Dec 03 06:47:58.590 INFO testing gotham-0.3.0 against master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61 for beta-1.31-5
Dec 03 06:47:58.590 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 06:47:59.059 INFO [stdout] b2553372c61a15f518aefb482924ab2cdb68e56e2b503f1b05b5ab5d35334bc9
Dec 03 06:47:59.061 INFO running `"docker" "start" "-a" "b2553372c61a15f518aefb482924ab2cdb68e56e2b503f1b05b5ab5d35334bc9"`
Dec 03 06:48:01.031 INFO [stderr] usermod: no changes
Dec 03 06:48:01.383 INFO [stderr]    Compiling cookie v0.11.0
Dec 03 06:48:01.420 INFO [stderr]    Compiling borrow-bag v1.0.0
Dec 03 06:48:01.422 INFO [stderr]    Compiling tokio-threadpool v0.1.9
Dec 03 06:48:01.427 INFO [stderr]    Compiling tokio-reactor v0.1.7
Dec 03 06:48:10.601 INFO [stderr]    Compiling tokio-udp v0.1.3
Dec 03 06:48:10.602 INFO [stderr]    Compiling tokio-uds v0.2.4
Dec 03 06:48:10.603 INFO [stderr]    Compiling tokio-tcp v0.1.2
Dec 03 06:48:15.101 INFO [stderr]    Compiling tokio-fs v0.1.4
Dec 03 06:48:23.797 INFO [stderr]    Compiling tokio v0.1.13
Dec 03 06:48:28.719 INFO [stderr]    Compiling hyper v0.12.16
Dec 03 06:48:40.623 INFO [stderr]    Compiling gotham v0.3.0 (/source)
Dec 03 06:48:57.910 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 56.84s
Dec 03 06:48:57.924 INFO [stderr] su: No module specific data is present
Dec 03 06:48:58.258 INFO running `"docker" "inspect" "b2553372c61a15f518aefb482924ab2cdb68e56e2b503f1b05b5ab5d35334bc9"`
Dec 03 06:48:58.397 INFO running `"docker" "rm" "-f" "b2553372c61a15f518aefb482924ab2cdb68e56e2b503f1b05b5ab5d35334bc9"`
Dec 03 06:48:58.484 INFO [stdout] b2553372c61a15f518aefb482924ab2cdb68e56e2b503f1b05b5ab5d35334bc9
Dec 03 06:48:58.486 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 06:48:58.766 INFO [stdout] 4a8e1f2918f1e9a5cad06220e87f2039c57506f88af772e88d52a063ad4852a7
Dec 03 06:48:58.768 INFO running `"docker" "start" "-a" "4a8e1f2918f1e9a5cad06220e87f2039c57506f88af772e88d52a063ad4852a7"`
Dec 03 06:48:59.699 INFO [stderr] usermod: no changes
Dec 03 06:48:59.907 INFO [stderr]    Compiling gotham_derive v0.3.0
Dec 03 06:49:04.739 INFO [stderr]    Compiling gotham v0.3.0 (/source)
Dec 03 06:49:31.359 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 31.63s
Dec 03 06:49:31.370 INFO [stderr] su: No module specific data is present
Dec 03 06:49:31.807 INFO running `"docker" "inspect" "4a8e1f2918f1e9a5cad06220e87f2039c57506f88af772e88d52a063ad4852a7"`
Dec 03 06:49:31.949 INFO running `"docker" "rm" "-f" "4a8e1f2918f1e9a5cad06220e87f2039c57506f88af772e88d52a063ad4852a7"`
Dec 03 06:49:32.099 INFO [stdout] 4a8e1f2918f1e9a5cad06220e87f2039c57506f88af772e88d52a063ad4852a7
Dec 03 06:49:32.105 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-7/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 06:49:32.431 INFO [stdout] ccfcf17eeea52ed834c81e34a9c70f317eac058b157f171641d3ff8b60bde165
Dec 03 06:49:32.436 INFO running `"docker" "start" "-a" "ccfcf17eeea52ed834c81e34a9c70f317eac058b157f171641d3ff8b60bde165"`
Dec 03 06:49:33.497 INFO [stderr] usermod: no changes
Dec 03 06:49:33.788 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.26s
Dec 03 06:49:33.834 INFO [stderr]      Running /target/debug/deps/gotham-61049264a80ae995
Dec 03 06:49:33.841 INFO [stdout] 
Dec 03 06:49:33.841 INFO [stdout] running 80 tests
Dec 03 06:49:33.843 INFO [stdout] test extractor::internal::tests::borrowed_bytes_path_tests ... ok
Dec 03 06:49:33.843 INFO [stdout] test extractor::internal::tests::enum_path_tests ... ok
Dec 03 06:49:33.843 INFO [stdout] test extractor::internal::tests::enum_query_tests ... ok
Dec 03 06:49:33.843 INFO [stdout] test extractor::internal::tests::byte_buf_values_query_tests ... ok
Dec 03 06:49:33.843 INFO [stdout] test extractor::internal::tests::byte_buf_values_path_tests ... ok
Dec 03 06:49:33.843 INFO [stdout] test extractor::internal::tests::borrowed_str_query_tests ... ok
Dec 03 06:49:33.843 INFO [stdout] test extractor::internal::tests::newtype_struct_query_tests ... ok
Dec 03 06:49:33.843 INFO [stdout] test extractor::internal::tests::newtype_struct_path_tests ... ok
Dec 03 06:49:33.843 INFO [stdout] test extractor::internal::tests::seq_query_tests ... ok
Dec 03 06:49:33.847 INFO [stdout] test extractor::internal::tests::borrowed_str_path_tests ... ok
Dec 03 06:49:33.847 INFO [stdout] test extractor::internal::tests::seq_path_tests ... ok
Dec 03 06:49:33.847 INFO [stdout] test extractor::internal::tests::borrowed_bytes_query_tests ... ok
Dec 03 06:49:33.847 INFO [stdout] test handler::assets::accepted_encoding::tests::accepted_encoding_multiple_values ... ok
Dec 03 06:49:33.848 INFO [stdout] test extractor::internal::tests::simple_values_path_tests ... ok
Dec 03 06:49:33.848 INFO [stdout] test handler::assets::accepted_encoding::tests::accepted_encoding_single ... ok
Dec 03 06:49:33.848 INFO [stdout] test handler::assets::accepted_encoding::tests::accepted_encoding_single_with_quality ... ok
Dec 03 06:49:33.848 INFO [stdout] test extractor::internal::tests::simple_values_query_tests ... ok
Dec 03 06:49:33.848 INFO [stdout] test handler::assets::accepted_encoding::tests::accepted_encoding_multiple_headers ... ok
Dec 03 06:49:34.072 INFO [stdout] test handler::assets::tests::assets_default_cache_control ... ok
Dec 03 06:49:34.111 INFO [stdout] test handler::assets::tests::assets_no_compression_if_not_accepted ... ok
Dec 03 06:49:34.111 INFO [stdout] test handler::assets::tests::assets_if_modified_since ... ok
Dec 03 06:49:34.187 INFO [stdout] test handler::assets::tests::assets_if_none_match_etag ... ok
Dec 03 06:49:34.199 INFO [stdout] test handler::assets::tests::assets_no_compression_if_not_exists ... ok
Dec 03 06:49:34.233 INFO [stdout] test helpers::http::request::path::tests::request_path_segments_tests ... ok
Dec 03 06:49:34.239 INFO [stdout] test helpers::http::tests::ensure_valid_percent_decode ... ok
Dec 03 06:49:34.256 INFO [stdout] test helpers::http::request::query_string::tests::query_string_mapping_tests ... ok
Dec 03 06:49:34.259 INFO [stdout] test helpers::http::tests::ensure_valid_www_form_url_encoded_value ... ok
Dec 03 06:49:34.280 INFO [stdout] test handler::assets::tests::assets_single_file ... ok
Dec 03 06:49:34.280 INFO [stdout] test middleware::session::backend::memory::tests::memory_backend_refresh_test ... ok
Dec 03 06:49:34.293 INFO [stdout] test handler::assets::tests::assets_with_cache_control ... ok
Dec 03 06:49:34.309 INFO [stdout] test middleware::session::backend::memory::tests::memory_backend_test ... ok
Dec 03 06:49:34.312 INFO [stdout] test middleware::session::backend::memory::tests::cleanup_test ... ok
Dec 03 06:49:34.312 INFO [stdout] test middleware::session::tests::enforce_host_cookie_prefix_attributes ... ok
Dec 03 06:49:34.313 INFO [stdout] test middleware::session::backend::memory::tests::cleanup_join_test ... ok
Dec 03 06:49:34.313 INFO [stdout] test middleware::session::tests::new_session_custom_settings ... ok
Dec 03 06:49:34.314 INFO [stdout] test middleware::session::tests::enforce_secure_cookie_prefix_attributes ... ok
Dec 03 06:49:34.324 INFO [stdout] test middleware::session::tests::new_session ... ok
Dec 03 06:49:34.324 INFO [stdout] test handler::assets::tests::assets_weighted_accept_encoding ... ok
Dec 03 06:49:34.325 INFO [stdout] test pipeline::single::tests::test_pipeline_construction ... ok
Dec 03 06:49:34.331 INFO [stdout] test handler::assets::tests::assets_compressed_if_accept_and_exists ... ok
Dec 03 06:49:34.343 INFO [stdout] test router::non_match::tests::deconstruct_tests ... ok
Dec 03 06:49:34.370 INFO [stdout] test middleware::session::tests::existing_session ... ok
Dec 03 06:49:34.381 INFO [stdout] test router::non_match::tests::union_tests ... ok
Dec 03 06:49:34.420 INFO [stdout] test router::non_match::tests::intersection_tests ... ok
Dec 03 06:49:34.421 INFO [stdout] test router::route::tests::external_route_tests ... ok
Dec 03 06:49:34.445 INFO [stdout] test router::builder::tests::build_router_test ... ok
Dec 03 06:49:34.461 INFO [stdout] test router::tests::custom_error_if_leaf_found_but_matching_route_not_found ... ok
Dec 03 06:49:34.466 INFO [stdout] test router::route::tests::internal_route_tests ... ok
Dec 03 06:49:34.521 INFO [stdout] test handler::assets::tests::assets_guesses_content_type ... ok
Dec 03 06:49:34.535 INFO [stdout] test router::tests::delegates_to_secondary_router ... ok
Dec 03 06:49:34.607 INFO [stdout] test router::tests::executes_response_finalizer_when_present ... ok
Dec 03 06:49:34.631 INFO [stdout] test router::tests::internal_server_error_if_no_request_path_segments ... ok
Dec 03 06:49:34.631 INFO [stdout] test router::tests::not_found_error_if_request_path_is_not_found ... ok
Dec 03 06:49:34.649 INFO [stdout] test pipeline::tests::pipeline_ordering_test ... ok
Dec 03 06:49:34.663 INFO [stdout] test router::tree::node::tests::node_traversal_tests ... ok
Dec 03 06:49:34.671 INFO [stdout] test router::builder::draw::tests::delegate_includes_pipelines ... ok
Dec 03 06:49:34.677 INFO [stdout] test router::tree::node::tests::traverses_children ... ok
Dec 03 06:49:34.677 INFO [stdout] test router::tree::node::tests::non_matching_routes_allow_list_tests ... ok
Dec 03 06:49:34.677 INFO [stdout] test router::tree::tests::tree_traversal_tests ... ok
Dec 03 06:49:34.692 INFO [stdout] test service::tests::router ... ok
Dec 03 06:49:34.696 INFO [stdout] test router::tree::node::tests::manages_children ... ok
Dec 03 06:49:34.697 INFO [stdout] test router::builder::draw::tests::delegate_without_pipelines_skips_pipelines ... ok
Dec 03 06:49:34.699 INFO [stdout] test router::tests::success_if_leaf_and_route_found ... ok
Dec 03 06:49:34.723 INFO [stdout] test service::trap::tests::error ... ok
Dec 03 06:49:34.724 INFO [stdout] test service::trap::tests::async_success_repeat_poll ... ok
Dec 03 06:49:34.725 INFO [stdout] test service::tests::new_handler_closure ... ok
Dec 03 06:49:34.738 INFO [stdout] test state::request_id::tests::does_not_overwrite_existant_request_id ... ok
Dec 03 06:49:34.739 INFO [stdout] test router::route::dispatch::tests::pipeline_chain_ordering_test ... ok
Dec 03 06:49:34.763 INFO [stdout] test service::trap::tests::success ... ok
Dec 03 06:49:34.763 INFO [stdout] test state::request_id::tests::sets_a_unique_request_id ... ok
Dec 03 06:49:34.763 INFO [stdout] test state::request_id::tests::uses_an_external_request_id ... ok
Dec 03 06:49:34.763 INFO [stdout] test test::tests::sets_client_addr ... ignored
Dec 03 06:49:34.763 INFO [stdout] test test::tests::times_out ... ignored
Dec 03 06:49:34.839 INFO [stdout] test test::tests::async_echo ... ok
Dec 03 06:49:34.875 INFO [stdout] test test::tests::serves_requests ... ok
Dec 03 06:49:34.955 INFO [stdout] test handler::assets::tests::assets_path_traversal ... ok
Dec 03 06:49:34.991 INFO [stdout] test service::trap::tests::async_panic_repeat_poll ... ok
Dec 03 06:49:34.992 INFO [stdout] test service::trap::tests::async_panic ... ok
Dec 03 06:49:34.996 INFO [stdout] test service::trap::tests::panic ... ok
Dec 03 06:49:34.996 INFO [stdout] test state::request_id::tests::panics_before_request_id_set ... ok
Dec 03 06:49:34.996 INFO [stdout] 
Dec 03 06:49:34.996 INFO [stdout] test result: ok. 78 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out
Dec 03 06:49:34.996 INFO [stdout] 
Dec 03 06:49:35.005 INFO [stderr]    Doc-tests gotham
Dec 03 06:49:46.563 INFO [stdout] 
Dec 03 06:49:46.563 INFO [stdout] running 101 tests
Dec 03 06:49:51.296 INFO [stdout] test src/extractor/internal.rs - extractor::internal::ExtractorError::UnexpectedEnumVariantType (line 45) ... ok
Dec 03 06:50:46.563 INFO [stdout] test src/handler/error.rs - handler::error::IntoHandlerError (line 22) ... test src/handler/error.rs - handler::error::IntoHandlerError (line 22) has been running for over 60 seconds
Dec 03 06:50:46.563 INFO [stdout] test src/extractor/path.rs - extractor::path::PathExtractor (line 21) ... test src/extractor/path.rs - extractor::path::PathExtractor (line 21) has been running for over 60 seconds
Dec 03 06:50:46.563 INFO [stdout] test src/handler/mod.rs - handler::Handler (line 121) ... test src/handler/mod.rs - handler::Handler (line 121) has been running for over 60 seconds
Dec 03 06:50:46.563 INFO [stdout] test src/handler/error.rs - handler::error::HandlerError::with_status (line 92) ... test src/handler/error.rs - handler::error::HandlerError::with_status (line 92) has been running for over 60 seconds
Dec 03 06:50:46.563 INFO [stdout] test src/handler/mod.rs - handler::Handler (line 48) ... test src/handler/mod.rs - handler::Handler (line 48) has been running for over 60 seconds
Dec 03 06:50:46.563 INFO [stdout] test src/handler/assets/mod.rs - handler::assets::FileOptions (line 56) ... test src/handler/assets/mod.rs - handler::assets::FileOptions (line 56) has been running for over 60 seconds
Dec 03 06:50:46.563 INFO [stdout] test src/extractor/query_string.rs - extractor::query_string::QueryStringExtractor (line 21) ... test src/extractor/query_string.rs - extractor::query_string::QueryStringExtractor (line 21) has been running for over 60 seconds
Dec 03 06:50:51.306 INFO [stdout] test src/handler/mod.rs - handler::Handler (line 71) ... test src/handler/mod.rs - handler::Handler (line 71) has been running for over 60 seconds
Dec 03 06:51:01.566 INFO [stdout] test src/handler/mod.rs - handler::Handler (line 121) ... ok
Dec 03 06:51:10.787 INFO [stdout] test src/handler/error.rs - handler::error::IntoHandlerError (line 22) ... ok
Dec 03 06:51:13.099 INFO [stdout] test src/handler/mod.rs - handler::Handler (line 48) ... ok
Dec 03 06:51:18.935 INFO [stdout] test src/handler/mod.rs - handler::Handler (line 71) ... ok
Dec 03 06:51:26.965 INFO [stdout] test src/handler/assets/mod.rs - handler::assets::FileOptions (line 56) ... ok
Dec 03 06:51:28.608 INFO [stdout] test src/handler/error.rs - handler::error::HandlerError::with_status (line 92) ... ok
Dec 03 06:51:33.999 INFO [stdout] test src/extractor/query_string.rs - extractor::query_string::QueryStringExtractor (line 21) ... ok
Dec 03 06:51:34.483 INFO [stdout] test src/extractor/path.rs - extractor::path::PathExtractor (line 21) ... ok
Dec 03 06:52:01.575 INFO [stdout] test src/handler/mod.rs - handler::Handler (line 93) ... test src/handler/mod.rs - handler::Handler (line 93) has been running for over 60 seconds
Dec 03 06:52:09.567 INFO [stdout] test src/handler/mod.rs - handler::Handler (line 93) ... ok
Dec 03 06:52:10.803 INFO [stdout] test src/handler/mod.rs - handler::IntoResponse (line 295) ... test src/handler/mod.rs - handler::IntoResponse (line 295) has been running for over 60 seconds
Dec 03 06:52:13.123 INFO [stdout] test src/handler/mod.rs - handler::NewHandler (line 177) ... test src/handler/mod.rs - handler::NewHandler (line 177) has been running for over 60 seconds
Dec 03 06:52:18.947 INFO [stdout] test src/handler/mod.rs - handler::NewHandler (line 211) ... test src/handler/mod.rs - handler::NewHandler (line 211) has been running for over 60 seconds
Dec 03 06:52:26.967 INFO [stdout] test src/helpers/http/response/mod.rs - helpers::http::response::create_empty_response (line 89) ... test src/helpers/http/response/mod.rs - helpers::http::response::create_empty_response (line 89) has been running for over 60 seconds
Dec 03 06:52:28.615 INFO [stdout] test src/helpers/http/response/mod.rs - helpers::http::response::create_permanent_redirect (line 133) ... test src/helpers/http/response/mod.rs - helpers::http::response::create_permanent_redirect (line 133) has been running for over 60 seconds
Dec 03 06:52:34.003 INFO [stdout] test src/helpers/http/response/mod.rs - helpers::http::response::create_response (line 19) ... test src/helpers/http/response/mod.rs - helpers::http::response::create_response (line 19) has been running for over 60 seconds
Dec 03 06:52:34.483 INFO [stdout] test src/helpers/http/response/mod.rs - helpers::http::response::create_temporary_redirect (line 177) ... test src/helpers/http/response/mod.rs - helpers::http::response::create_temporary_redirect (line 177) has been running for over 60 seconds
Dec 03 06:52:35.439 INFO [stdout] test src/handler/mod.rs - handler::NewHandler (line 177) ... ok
Dec 03 06:52:45.602 INFO [stdout] test src/handler/mod.rs - handler::NewHandler (line 211) ... ok
Dec 03 06:52:59.991 INFO [stdout] test src/handler/mod.rs - handler::IntoResponse (line 295) ... ok
Dec 03 06:53:09.567 INFO [stdout] test src/middleware/mod.rs - middleware::Middleware (line 140) ... test src/middleware/mod.rs - middleware::Middleware (line 140) has been running for over 60 seconds
Dec 03 06:53:18.691 INFO [stdout] test src/helpers/http/response/mod.rs - helpers::http::response::create_empty_response (line 89) ... ok
Dec 03 06:53:18.895 INFO [stdout] test src/helpers/http/response/mod.rs - helpers::http::response::create_permanent_redirect (line 133) ... ok
Dec 03 06:53:34.255 INFO [stdout] test src/helpers/http/response/mod.rs - helpers::http::response::create_response (line 19) ... ok
Dec 03 06:53:34.387 INFO [stdout] test src/helpers/http/response/mod.rs - helpers::http::response::create_temporary_redirect (line 177) ... ok
Dec 03 06:53:35.443 INFO [stdout] test src/middleware/mod.rs - middleware::Middleware (line 203) ... test src/middleware/mod.rs - middleware::Middleware (line 203) has been running for over 60 seconds
Dec 03 06:53:45.610 INFO [stdout] test src/middleware/mod.rs - middleware::Middleware (line 264) ... test src/middleware/mod.rs - middleware::Middleware (line 264) has been running for over 60 seconds
Dec 03 06:54:00.003 INFO [stdout] test src/middleware/mod.rs - middleware::Middleware (line 30) ... test src/middleware/mod.rs - middleware::Middleware (line 30) has been running for over 60 seconds
Dec 03 06:54:14.151 INFO [stdout] test src/middleware/mod.rs - middleware::Middleware (line 140) ... ok
Dec 03 06:54:18.687 INFO [stdout] test src/middleware/mod.rs - middleware::Middleware (line 79) ... test src/middleware/mod.rs - middleware::Middleware (line 79) has been running for over 60 seconds
Dec 03 06:54:18.887 INFO [stdout] test src/middleware/mod.rs - middleware::NewMiddleware (line 336) ... test src/middleware/mod.rs - middleware::NewMiddleware (line 336) has been running for over 60 seconds
Dec 03 06:54:32.587 INFO [stdout] test src/middleware/mod.rs - middleware::Middleware (line 203) ... ok
Dec 03 06:54:34.255 INFO [stdout] test src/middleware/session/backend/memory.rs - middleware::session::backend::memory::MemoryBackend::new (line 41) ... test src/middleware/session/backend/memory.rs - middleware::session::backend::memory::MemoryBackend::new (line 41) has been running for over 60 seconds
Dec 03 06:54:34.391 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 414) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 414) has been running for over 60 seconds
Dec 03 06:54:55.919 INFO [stdout] test src/middleware/mod.rs - middleware::Middleware (line 264) ... ok
Dec 03 06:55:04.545 INFO [stdout] test src/middleware/mod.rs - middleware::Middleware (line 30) ... ok
Dec 03 06:55:07.757 INFO [stdout] test src/middleware/mod.rs - middleware::NewMiddleware (line 336) ... ok
Dec 03 06:55:14.155 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 425) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 425) has been running for over 60 seconds
Dec 03 06:55:19.966 INFO [stdout] test src/middleware/mod.rs - middleware::Middleware (line 79) ... ok
Dec 03 06:55:23.483 INFO [stdout] test src/middleware/session/backend/memory.rs - middleware::session::backend::memory::MemoryBackend::new (line 41) ... ok
Dec 03 06:55:32.607 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 436) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 436) has been running for over 60 seconds
Dec 03 06:55:32.903 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 414) ... ok
Dec 03 06:55:55.918 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::allow_cross_site_usage (line 696) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::allow_cross_site_usage (line 696) has been running for over 60 seconds
Dec 03 06:56:04.551 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::insecure (line 585) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::insecure (line 585) has been running for over 60 seconds
Dec 03 06:56:07.755 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_cookie_domain (line 658) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_cookie_domain (line 658) has been running for over 60 seconds
Dec 03 06:56:13.979 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 425) ... ok
Dec 03 06:56:19.959 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_cookie_name (line 627) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_cookie_name (line 627) has been running for over 60 seconds
Dec 03 06:56:23.483 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_cookie_path (line 553) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_cookie_path (line 553) has been running for over 60 seconds
Dec 03 06:56:31.355 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware (line 436) ... ok
Dec 03 06:56:32.903 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_session_type (line 761) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_session_type (line 761) has been running for over 60 seconds
Dec 03 06:56:55.471 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::allow_cross_site_usage (line 696) ... ok
Dec 03 06:57:03.555 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::insecure (line 585) ... ok
Dec 03 06:57:06.339 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_cookie_domain (line 658) ... ok
Dec 03 06:57:14.019 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_strict_same_site_enforcement (line 732) ... test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_strict_same_site_enforcement (line 732) has been running for over 60 seconds
Dec 03 06:57:20.583 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_cookie_name (line 627) ... ok
Dec 03 06:57:30.519 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_cookie_path (line 553) ... ok
Dec 03 06:57:31.359 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::SessionData (line 189) ... test src/middleware/session/mod.rs - middleware::session::SessionData (line 189) has been running for over 60 seconds
Dec 03 06:57:39.375 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_session_type (line 761) ... ok
Dec 03 06:57:55.479 INFO [stdout] test src/pipeline/mod.rs - pipeline::Pipeline (line 23) ... test src/pipeline/mod.rs - pipeline::Pipeline (line 23) has been running for over 60 seconds
Dec 03 06:58:03.554 INFO [stdout] test src/pipeline/mod.rs - pipeline::PipelineBuilder (line 185) ... test src/pipeline/mod.rs - pipeline::PipelineBuilder (line 185) has been running for over 60 seconds
Dec 03 06:58:04.785 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::NewSessionMiddleware<B, T>::with_strict_same_site_enforcement (line 732) ... ok
Dec 03 06:58:06.351 INFO [stdout] test src/pipeline/single.rs - pipeline::single::single_pipeline (line 26) ... test src/pipeline/single.rs - pipeline::single::single_pipeline (line 26) has been running for over 60 seconds
Dec 03 06:58:20.594 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::add_route_matcher (line 71) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::add_route_matcher (line 71) has been running for over 60 seconds
Dec 03 06:58:27.559 INFO [stdout] test src/middleware/session/mod.rs - middleware::session::SessionData (line 189) ... ok
Dec 03 06:58:30.538 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::delete (line 609) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::delete (line 609) has been running for over 60 seconds
Dec 03 06:58:39.379 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::get (line 434) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::get (line 434) has been running for over 60 seconds
Dec 03 06:58:48.947 INFO [stdout] test src/pipeline/mod.rs - pipeline::PipelineBuilder (line 185) ... ok
Dec 03 06:59:02.783 INFO [stdout] test src/pipeline/single.rs - pipeline::single::single_pipeline (line 26) ... ok
Dec 03 06:59:03.235 INFO [stdout] test src/pipeline/mod.rs - pipeline::Pipeline (line 23) ... ok
Dec 03 06:59:04.787 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::get_or_head (line 384) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::get_or_head (line 384) has been running for over 60 seconds
Dec 03 06:59:15.919 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::add_route_matcher (line 71) ... ok
Dec 03 06:59:27.579 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::head (line 341) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::head (line 341) has been running for over 60 seconds
Dec 03 06:59:30.039 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::delete (line 609) ... ok
Dec 03 06:59:33.155 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::get (line 434) ... ok
Dec 03 06:59:48.951 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::options (line 652) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::options (line 652) has been running for over 60 seconds
Dec 03 07:00:02.785 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::patch (line 565) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::patch (line 565) has been running for over 60 seconds
Dec 03 07:00:03.235 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::post (line 477) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::post (line 477) has been running for over 60 seconds
Dec 03 07:00:03.907 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::get_or_head (line 384) ... ok
Dec 03 07:00:15.923 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::put (line 521) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::put (line 521) has been running for over 60 seconds
Dec 03 07:00:30.055 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::request (line 269) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::request (line 269) has been running for over 60 seconds
Dec 03 07:00:33.151 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::with_path_extractor (line 139) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::with_path_extractor (line 139) has been running for over 60 seconds
Dec 03 07:00:41.887 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::head (line 341) ... ok
Dec 03 07:00:55.222 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::options (line 652) ... ok
Dec 03 07:01:01.455 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::post (line 477) ... ok
Dec 03 07:01:03.907 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::with_query_string_extractor (line 203) ... test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::with_query_string_extractor (line 203) has been running for over 60 seconds
Dec 03 07:01:06.971 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::patch (line 565) ... ok
Dec 03 07:01:16.007 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::put (line 521) ... ok
Dec 03 07:01:41.887 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::associate (line 786) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::associate (line 786) has been running for over 60 seconds
Dec 03 07:01:43.823 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::request (line 269) ... ok
Dec 03 07:01:48.003 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::with_path_extractor (line 139) ... ok
Dec 03 07:01:55.227 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate (line 652) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate (line 652) has been running for over 60 seconds
Dec 03 07:02:01.455 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate_without_pipelines (line 704) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate_without_pipelines (line 704) has been running for over 60 seconds
Dec 03 07:02:06.983 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delete (line 287) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delete (line 287) has been running for over 60 seconds
Dec 03 07:02:12.806 INFO [stdout] test src/router/builder/associated.rs - router::builder::associated::AssociatedRouteBuilder<'a, M, C, P, PE, QSE>::with_query_string_extractor (line 203) ... ok
Dec 03 07:02:16.007 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get (line 99) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get (line 99) has been running for over 60 seconds
Dec 03 07:02:33.643 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::associate (line 786) ... ok
Dec 03 07:02:43.839 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get_or_head (line 55) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get_or_head (line 55) has been running for over 60 seconds
Dec 03 07:02:48.006 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::head (line 136) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::head (line 136) has been running for over 60 seconds
Dec 03 07:02:53.227 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate (line 652) ... ok
Dec 03 07:02:59.527 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delegate_without_pipelines (line 704) ... ok
Dec 03 07:03:12.807 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::options (line 324) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::options (line 324) has been running for over 60 seconds
Dec 03 07:03:14.217 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get (line 99) ... ok
Dec 03 07:03:15.427 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::delete (line 287) ... ok
Dec 03 07:03:33.639 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::patch (line 249) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::patch (line 249) has been running for over 60 seconds
Dec 03 07:03:40.152 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::get_or_head (line 55) ... ok
Dec 03 07:03:45.803 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::head (line 136) ... ok
Dec 03 07:03:53.235 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::post (line 173) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::post (line 173) has been running for over 60 seconds
Dec 03 07:03:59.523 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::put (line 211) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::put (line 211) has been running for over 60 seconds
Dec 03 07:04:09.987 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::options (line 324) ... ok
Dec 03 07:04:14.231 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::request (line 365) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::request (line 365) has been running for over 60 seconds
Dec 03 07:04:15.435 INFO [stdout] test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::request (line 403) ... test src/router/builder/draw.rs - router::builder::draw::DrawRoutes::request (line 403) has been running for over 60 seconds
Dec 03 07:04:32.452 ERRO error running command: command timed out after 900 seconds
Dec 03 07:04:32.452 INFO running `"docker" "inspect" "ccfcf17eeea52ed834c81e34a9c70f317eac058b157f171641d3ff8b60bde165"`
Dec 03 07:04:32.707 INFO running `"docker" "rm" "-f" "ccfcf17eeea52ed834c81e34a9c70f317eac058b157f171641d3ff8b60bde165"`
Dec 03 07:04:33.804 INFO [stdout] ccfcf17eeea52ed834c81e34a9c70f317eac058b157f171641d3ff8b60bde165
